[INFO] cloning repository https://github.com/bjansen/ruboy
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/bjansen/ruboy" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fbjansen%2Fruboy", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fbjansen%2Fruboy'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] b3e5dcb1836d256fb4e526ff42898fa9a9cf0bd7
[INFO] testing bjansen/ruboy against try#0abe69e6c16114311cc2700e972492e64d69c28f for pr-154065
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fbjansen%2Fruboy" "/workspace/builds/worker-0-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-0-tc2/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/bjansen/ruboy
[INFO] finished tweaking git repo https://github.com/bjansen/ruboy
[INFO] tweaked toml for git repo https://github.com/bjansen/ruboy written to /workspace/builds/worker-0-tc2/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/bjansen/ruboy on toolchain 0abe69e6c16114311cc2700e972492e64d69c28f
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/bjansen/ruboy already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] daee1bd93e2a7d6c5f4c9f5e018fcb6ef5aee92241496a383dd07cb74f63a0fb
[INFO] running `Command { std: "docker" "start" "-a" "daee1bd93e2a7d6c5f4c9f5e018fcb6ef5aee92241496a383dd07cb74f63a0fb", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "daee1bd93e2a7d6c5f4c9f5e018fcb6ef5aee92241496a383dd07cb74f63a0fb", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "daee1bd93e2a7d6c5f4c9f5e018fcb6ef5aee92241496a383dd07cb74f63a0fb", kill_on_drop: false }`
[INFO] [stdout] daee1bd93e2a7d6c5f4c9f5e018fcb6ef5aee92241496a383dd07cb74f63a0fb
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] d551fb6c513a2790af6167672a4344019f781a0b91759c16940a2b4356611a4b
[INFO] running `Command { std: "docker" "start" "-a" "d551fb6c513a2790af6167672a4344019f781a0b91759c16940a2b4356611a4b", kill_on_drop: false }`
[INFO] [stderr]    Compiling ruboy v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.31s
[INFO] running `Command { std: "docker" "inspect" "d551fb6c513a2790af6167672a4344019f781a0b91759c16940a2b4356611a4b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d551fb6c513a2790af6167672a4344019f781a0b91759c16940a2b4356611a4b", kill_on_drop: false }`
[INFO] [stdout] d551fb6c513a2790af6167672a4344019f781a0b91759c16940a2b4356611a4b
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] c6006b763404ef6beba8b336986cc0394ae60234d026bbdb77cf867c55b94b33
[INFO] running `Command { std: "docker" "start" "-a" "c6006b763404ef6beba8b336986cc0394ae60234d026bbdb77cf867c55b94b33", kill_on_drop: false }`
[INFO] [stderr]    Compiling ruboy v0.1.0 (/opt/rustwide/workdir)
[INFO] [stdout] warning: function `assert_flags_eq` is never used
[INFO] [stdout]   --> tests/common/mod.rs:14:8
[INFO] [stdout]    |
[INFO] [stdout] 14 | pub fn assert_flags_eq(cpu: &Cpu, z: bool, n: bool, h: bool, c: bool) {
[INFO] [stdout]    |        ^^^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: function `assert_flags_eq` is never used
[INFO] [stdout]   --> tests/common/mod.rs:14:8
[INFO] [stdout]    |
[INFO] [stdout] 14 | pub fn assert_flags_eq(cpu: &Cpu, z: bool, n: bool, h: bool, c: bool) {
[INFO] [stdout]    |        ^^^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: function `assert_flags_eq` is never used
[INFO] [stdout]   --> tests/common/mod.rs:14:8
[INFO] [stdout]    |
[INFO] [stdout] 14 | pub fn assert_flags_eq(cpu: &Cpu, z: bool, n: bool, h: bool, c: bool) {
[INFO] [stdout]    |        ^^^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: function `build_cartridge` is never used
[INFO] [stdout]  --> tests/common/mod.rs:4:8
[INFO] [stdout]   |
[INFO] [stdout] 4 | pub fn build_cartridge(program: Vec<u8>) -> Cartridge {
[INFO] [stdout]   |        ^^^^^^^^^^^^^^^
[INFO] [stdout]   |
[INFO] [stdout]   = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: function `assert_flags_eq` is never used
[INFO] [stdout]   --> tests/common/mod.rs:14:8
[INFO] [stdout]    |
[INFO] [stdout] 14 | pub fn assert_flags_eq(cpu: &Cpu, z: bool, n: bool, h: bool, c: bool) {
[INFO] [stdout]    |        ^^^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: function `assert_flags_eq` is never used
[INFO] [stdout]   --> tests/common/mod.rs:14:8
[INFO] [stdout]    |
[INFO] [stdout] 14 | pub fn assert_flags_eq(cpu: &Cpu, z: bool, n: bool, h: bool, c: bool) {
[INFO] [stdout]    |        ^^^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: function `assert_flags_eq` is never used
[INFO] [stdout]   --> tests/common/mod.rs:14:8
[INFO] [stdout]    |
[INFO] [stdout] 14 | pub fn assert_flags_eq(cpu: &Cpu, z: bool, n: bool, h: bool, c: bool) {
[INFO] [stdout]    |        ^^^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: function `assert_flags_eq` is never used
[INFO] [stdout]   --> tests/common/mod.rs:14:8
[INFO] [stdout]    |
[INFO] [stdout] 14 | pub fn assert_flags_eq(cpu: &Cpu, z: bool, n: bool, h: bool, c: bool) {
[INFO] [stdout]    |        ^^^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: function `assert_flags_eq` is never used
[INFO] [stdout]   --> tests/common/mod.rs:14:8
[INFO] [stdout]    |
[INFO] [stdout] 14 | pub fn assert_flags_eq(cpu: &Cpu, z: bool, n: bool, h: bool, c: bool) {
[INFO] [stdout]    |        ^^^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: function `assert_flags_eq` is never used
[INFO] [stdout]   --> tests/common/mod.rs:14:8
[INFO] [stdout]    |
[INFO] [stdout] 14 | pub fn assert_flags_eq(cpu: &Cpu, z: bool, n: bool, h: bool, c: bool) {
[INFO] [stdout]    |        ^^^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: function `assert_flags_eq` is never used
[INFO] [stdout]   --> tests/common/mod.rs:14:8
[INFO] [stdout]    |
[INFO] [stdout] 14 | pub fn assert_flags_eq(cpu: &Cpu, z: bool, n: bool, h: bool, c: bool) {
[INFO] [stdout]    |        ^^^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: function `assert_flags_eq` is never used
[INFO] [stdout]   --> tests/common/mod.rs:14:8
[INFO] [stdout]    |
[INFO] [stdout] 14 | pub fn assert_flags_eq(cpu: &Cpu, z: bool, n: bool, h: bool, c: bool) {
[INFO] [stdout]    |        ^^^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: function `assert_flags_eq` is never used
[INFO] [stdout]   --> tests/common/mod.rs:14:8
[INFO] [stdout]    |
[INFO] [stdout] 14 | pub fn assert_flags_eq(cpu: &Cpu, z: bool, n: bool, h: bool, c: bool) {
[INFO] [stdout]    |        ^^^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: function `assert_flags_eq` is never used
[INFO] [stdout]   --> tests/common/mod.rs:14:8
[INFO] [stdout]    |
[INFO] [stdout] 14 | pub fn assert_flags_eq(cpu: &Cpu, z: bool, n: bool, h: bool, c: bool) {
[INFO] [stdout]    |        ^^^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 4.90s
[INFO] running `Command { std: "docker" "inspect" "c6006b763404ef6beba8b336986cc0394ae60234d026bbdb77cf867c55b94b33", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c6006b763404ef6beba8b336986cc0394ae60234d026bbdb77cf867c55b94b33", kill_on_drop: false }`
[INFO] [stdout] c6006b763404ef6beba8b336986cc0394ae60234d026bbdb77cf867c55b94b33
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 1af45c31d7b4e3ec4184ee971a0155d34dcdf55aa5abe93e95a74bd6c570880a
[INFO] running `Command { std: "docker" "start" "-a" "1af45c31d7b4e3ec4184ee971a0155d34dcdf55aa5abe93e95a74bd6c570880a", kill_on_drop: false }`
[INFO] [stderr] warning: function `assert_flags_eq` is never used
[INFO] [stderr]   --> tests/common/mod.rs:14:8
[INFO] [stderr]    |
[INFO] [stderr] 14 | pub fn assert_flags_eq(cpu: &Cpu, z: bool, n: bool, h: bool, c: bool) {
[INFO] [stderr]    |        ^^^^^^^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: `ruboy` (test "test_daa") generated 1 warning
[INFO] [stderr] warning: `ruboy` (test "test_call") generated 1 warning (1 duplicate)
[INFO] [stderr] warning: `ruboy` (test "test_misc") generated 1 warning (1 duplicate)
[INFO] [stderr] warning: `ruboy` (test "test_stack") generated 1 warning (1 duplicate)
[INFO] [stderr] warning: `ruboy` (test "test_ret") generated 1 warning (1 duplicate)
[INFO] [stderr] warning: `ruboy` (test "test_res") generated 1 warning (1 duplicate)
[INFO] [stderr] warning: `ruboy` (test "test_8bit_alu") generated 1 warning (1 duplicate)
[INFO] [stderr] warning: `ruboy` (test "test_jump") generated 1 warning (1 duplicate)
[INFO] [stderr] warning: `ruboy` (test "test_ld") generated 1 warning (1 duplicate)
[INFO] [stderr] warning: function `build_cartridge` is never used
[INFO] [stderr]  --> tests/common/mod.rs:4:8
[INFO] [stderr]   |
[INFO] [stderr] 4 | pub fn build_cartridge(program: Vec<u8>) -> Cartridge {
[INFO] [stderr]   |        ^^^^^^^^^^^^^^^
[INFO] [stderr]   |
[INFO] [stderr]   = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: `ruboy` (test "test_flags") generated 1 warning
[INFO] [stderr] warning: `ruboy` (test "test_restart") generated 1 warning (1 duplicate)
[INFO] [stderr] warning: `ruboy` (test "test_set") generated 1 warning (1 duplicate)
[INFO] [stderr] warning: `ruboy` (test "test_16bit_arithmetic") generated 1 warning (1 duplicate)
[INFO] [stderr] warning: `ruboy` (test "test_bit") generated 1 warning (1 duplicate)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.03s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/ruboy-ae4feddffc3b5620)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_16bit_arithmetic.rs (/opt/rustwide/target/debug/deps/test_16bit_arithmetic-ba70d12e0b3735b2)
[INFO] [stdout] 
[INFO] [stdout] running 13 tests
[INFO] [stdout] test test_ADD_SPn ... ok
[INFO] [stdout] test test_ADD_HL_DE ... ok
[INFO] [stdout] test test_DEC_BC ... ok
[INFO] [stdout] test test_DEC_DE ... ok
[INFO] [stdout] test test_DEC_HL ... ok
[INFO] [stdout] test test_DEC_SP ... ok
[INFO] [stdout] test test_INC_BC ... ok
[INFO] [stdout] test test_ADD_HL_BC ... ok
[INFO] [stdout] test test_ADD_HL_SP ... ok
[INFO] [stdout] test test_ADD_HL_HL ... ok
[INFO] [stdout] test test_INC_HL ... ok
[INFO] [stdout] test test_INC_DE ... ok
[INFO] [stderr]      Running tests/test_8bit_alu.rs (/opt/rustwide/target/debug/deps/test_8bit_alu-3bb64480b81577b4)
[INFO] [stdout] test test_INC_SP ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 89 tests
[INFO] [stdout] test test_ADC_AD ... ok
[INFO] [stdout] test test_ADC_AB ... ok
[INFO] [stdout] test test_ADC_AE ... ok
[INFO] [stdout] test test_ADC_AA ... ok
[INFO] [stdout] test test_ADC_AC ... ok
[INFO] [stdout] test test_ADC_AHL ... ok
[INFO] [stdout] test test_ADD_AA ... ok
[INFO] [stdout] test test_ADD_AC ... ok
[INFO] [stdout] test test_ADD_AB ... ok
[INFO] [stdout] test test_ADD_AD ... ok
[INFO] [stdout] test test_ADD_AE ... ok
[INFO] [stdout] test test_ADD_AH ... ok
[INFO] [stdout] test test_ADD_AL ... ok
[INFO] [stdout] test test_ADC_AH ... ok
[INFO] [stdout] test test_ADD_An ... ok
[INFO] [stdout] test test_ADD_flags ... ok
[INFO] [stdout] test test_ADC_AL ... ok
[INFO] [stdout] test test_AND_AA ... ok
[INFO] [stdout] test test_AND_AB ... ok
[INFO] [stdout] test test_AND_AE ... ok
[INFO] [stdout] test test_AND_AH ... ok
[INFO] [stdout] test test_AND_AC ... ok
[INFO] [stdout] test test_AND_AD ... ok
[INFO] [stdout] test test_AND_AL ... ok
[INFO] [stdout] test test_AND_An ... ok
[INFO] [stdout] test test_CP_B ... ok
[INFO] [stdout] test test_CP_E ... ok
[INFO] [stdout] test test_CP_C ... ok
[INFO] [stdout] test test_CP_A ... ok
[INFO] [stdout] test test_CP_H ... ok
[INFO] [stdout] test test_CP_D ... ok
[INFO] [stdout] test test_ADD_AHL ... ok
[INFO] [stdout] test test_DEC_A ... ok
[INFO] [stdout] test test_ADC_An ... ok
[INFO] [stdout] test test_AND_AHL ... ok
[INFO] [stdout] test test_DEC_B ... ok
[INFO] [stdout] test test_DEC_H ... ok
[INFO] [stdout] test test_DEC_HL ... ok
[INFO] [stdout] test test_DEC_L ... ok
[INFO] [stdout] test test_INC_A ... ok
[INFO] [stdout] test test_INC_B ... ok
[INFO] [stdout] test test_INC_C ... ok
[INFO] [stdout] test test_INC_D ... ok
[INFO] [stdout] test test_INC_E ... ok
[INFO] [stdout] test test_INC_H ... ok
[INFO] [stdout] test test_INC_HL ... ok
[INFO] [stdout] test test_INC_L ... ok
[INFO] [stdout] test test_OR_AA ... ok
[INFO] [stdout] test test_OR_AB ... ok
[INFO] [stdout] test test_OR_AC ... ok
[INFO] [stdout] test test_OR_AD ... ok
[INFO] [stdout] test test_OR_AE ... ok
[INFO] [stdout] test test_CP_HL ... ok
[INFO] [stderr]      Running tests/test_bit.rs (/opt/rustwide/target/debug/deps/test_bit-918dcfb13b5e4732)
[INFO] [stdout] test test_OR_AHL ... ok
[INFO] [stdout] test test_OR_AL ... ok
[INFO] [stdout] test test_OR_AH ... ok
[INFO] [stdout] test test_OR_An ... ok
[INFO] [stdout] test test_SBC_AHL ... ok
[INFO] [stdout] test test_SBC_A ... ok
[INFO] [stdout] test test_SBC_An ... ok
[INFO] [stdout] test test_SBC_B ... ok
[INFO] [stdout] test test_SBC_C ... ok
[INFO] [stdout] test test_SBC_E ... ok
[INFO] [stdout] test test_SBC_D ... ok
[INFO] [stdout] test test_SBC_H ... ok
[INFO] [stdout] test test_SBC_L ... ok
[INFO] [stdout] test test_SUB_A ... ok
[INFO] [stdout] test test_DEC_C ... ok
[INFO] [stdout] test test_SUB_AHL ... ok
[INFO] [stdout] test test_DEC_D ... ok
[INFO] [stdout] test test_DEC_E ... ok
[INFO] [stdout] test test_SUB_An ... ok
[INFO] [stdout] test test_SUB_C ... ok
[INFO] [stdout] test test_SUB_B ... ok
[INFO] [stdout] test test_SUB_E ... ok
[INFO] [stdout] test test_SUB_H ... ok
[INFO] [stdout] test test_XOR_AA ... ok
[INFO] [stdout] test test_XOR_AB ... ok
[INFO] [stdout] test test_XOR_AC ... ok
[INFO] [stdout] test test_XOR_AD ... ok
[INFO] [stdout] test test_XOR_AE ... ok
[INFO] [stdout] test test_XOR_AH ... ok
[INFO] [stdout] test test_XOR_AHL ... ok
[INFO] [stdout] test test_XOR_AL ... ok
[INFO] [stdout] test test_XOR_An ... ok
[INFO] [stdout] test test_SUB_L ... ok
[INFO] [stdout] test test_SUB_D ... ok
[INFO] [stdout] test test_CP_L ... ok
[INFO] [stdout] test test_CP_n ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 89 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 64 tests
[INFO] [stdout] test test_BIT_0B ... ok
[INFO] [stdout] test test_BIT_0D ... ok
[INFO] [stdout] test test_BIT_0A ... ok
[INFO] [stdout] test test_BIT_0C ... ok
[INFO] [stdout] test test_BIT_0E ... ok
[INFO] [stdout] test test_BIT_0HL ... ok
[INFO] [stdout] test test_BIT_0H ... ok
[INFO] [stdout] test test_BIT_0L ... ok
[INFO] [stdout] test test_BIT_1B ... ok
[INFO] [stdout] test test_BIT_1D ... ok
[INFO] [stdout] test test_BIT_1E ... ok
[INFO] [stdout] test test_BIT_1HL ... ok
[INFO] [stdout] test test_BIT_1L ... ok
[INFO] [stdout] test test_BIT_2A ... ok
[INFO] [stdout] test test_BIT_2C ... ok
[INFO] [stdout] test test_BIT_2D ... ok
[INFO] [stdout] test test_BIT_2E ... ok
[INFO] [stdout] test test_BIT_2L ... ok
[INFO] [stdout] test test_BIT_1H ... ok
[INFO] [stdout] test test_BIT_1A ... ok
[INFO] [stdout] test test_BIT_1C ... ok
[INFO] [stdout] test test_BIT_2B ... ok
[INFO] [stdout] test test_BIT_3A ... ok
[INFO] [stdout] test test_BIT_3B ... ok
[INFO] [stdout] test test_BIT_3C ... ok
[INFO] [stdout] test test_BIT_3E ... ok
[INFO] [stdout] test test_BIT_3D ... ok
[INFO] [stdout] test test_BIT_4A ... ok
[INFO] [stdout] test test_BIT_3HL ... ok
[INFO] [stdout] test test_BIT_2H ... ok
[INFO] [stdout] test test_BIT_3H ... ok
[INFO] [stdout] test test_BIT_4E ... ok
[INFO] [stdout] test test_BIT_4D ... ok
[INFO] [stdout] test test_BIT_4H ... ok
[INFO] [stdout] test test_BIT_4HL ... ok
[INFO] [stdout] test test_BIT_4B ... ok
[INFO] [stdout] test test_BIT_2HL ... ok
[INFO] [stdout] test test_BIT_4C ... ok
[INFO] [stdout] test test_BIT_3L ... ok
[INFO] [stdout] test test_BIT_5D ... ok
[INFO] [stdout] test test_BIT_5E ... ok
[INFO] [stdout] test test_BIT_4L ... ok
[INFO] [stdout] test test_BIT_5A ... ok
[INFO] [stdout] test test_BIT_5C ... ok
[INFO] [stdout] test test_BIT_5H ... ok
[INFO] [stdout] test test_BIT_5B ... ok
[INFO] [stdout] test test_BIT_6B ... ok
[INFO] [stdout] test test_BIT_6C ... ok
[INFO] [stdout] test test_BIT_6D ... ok
[INFO] [stdout] test test_BIT_6HL ... ok
[INFO] [stdout] test test_BIT_5HL ... ok
[INFO] [stdout] test test_BIT_5L ... ok
[INFO] [stdout] test test_BIT_6L ... ok
[INFO] [stdout] test test_BIT_6A ... ok
[INFO] [stdout] test test_BIT_6H ... ok
[INFO] [stdout] test test_BIT_7D ... ok
[INFO] [stdout] test test_BIT_7E ... ok
[INFO] [stdout] test test_BIT_7L ... ok
[INFO] [stdout] test test_BIT_7B ... ok
[INFO] [stdout] test test_BIT_7C ... ok
[INFO] [stdout] test test_BIT_7H ... ok
[INFO] [stdout] test test_BIT_7HL ... ok
[INFO] [stdout] test test_BIT_7A ... ok
[INFO] [stdout] test test_BIT_6E ... ok
[INFO] [stderr]      Running tests/test_blargg.rs (/opt/rustwide/target/debug/deps/test_blargg-7660486e350eb7be)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 64 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.19s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 12 tests
[INFO] [stdout] test test_blargg_cpu_instrs_07 ... ok
[INFO] [stdout] test test_blargg_cpu_instrs_06 ... ok
[INFO] [stdout] test test_blargg_cpu_instrs_02 ... FAILED
[INFO] [stdout] test test_blargg_cpu_instrs_08 ... ok
[INFO] [stdout] test test_blargg_cpu_instrs_03 ... ok
[INFO] [stdout] test test_blargg_cpu_instrs_01 ... ok
[INFO] [stdout] test test_blargg_cpu_instrs_04 ... ok
[INFO] [stdout] test test_blargg_cpu_instrs_05 ... ok
[INFO] [stdout] test test_blargg_cpu_instrs ... FAILED
[INFO] [stdout] test test_blargg_cpu_instrs_09 ... ok
[INFO] [stdout] test test_blargg_cpu_instrs_10 ... ok
[INFO] [stdout] test test_blargg_cpu_instrs_11 ... ok
[INFO] [stderr] error: test failed, to rerun pass `--test test_blargg`
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- test_blargg_cpu_instrs_02 stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'test_blargg_cpu_instrs_02' (189) panicked at tests/test_blargg.rs:153:5:
[INFO] [stdout] assertion `left == right` failed: Expected screen output not to contain the word 'Failed'. Screen output:
[INFO] [stdout] ---
[INFO] [stdout] 02-interrupts                                                                                   EI                                                              Failed #2                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                      
[INFO] [stdout] ---
[INFO] [stdout] 
[INFO] [stdout]   left: false
[INFO] [stdout]  right: true
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5b1bd3efe88a - std[ec4e911328de40a6]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5b1bd3efe88a - std[ec4e911328de40a6]::backtrace_rs::backtrace::trace_unsynchronized::<std[ec4e911328de40a6]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5b1bd3efe88a - std[ec4e911328de40a6]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5b1bd3efe88a - <<std[ec4e911328de40a6]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a96a4c5c53f902a3]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5b1bd3f1253a - <core[a96a4c5c53f902a3]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5b1bd3f1253a - core[a96a4c5c53f902a3]::fmt::write
[INFO] [stdout]    6:     0x5b1bd3f03112 - std[ec4e911328de40a6]::io::default_write_fmt::<alloc[c960326de6de28e6]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x5b1bd3f03112 - <alloc[c960326de6de28e6]::vec::Vec<u8> as std[ec4e911328de40a6]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x5b1bd3edd7af - <std[ec4e911328de40a6]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5b1bd3edd7af - std[ec4e911328de40a6]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5b1bd3ef6b49 - std[ec4e911328de40a6]::panicking::default_hook
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5b1bd3e7daec - <alloc[c960326de6de28e6]::boxed::Box<dyn for<'a, 'b> core[a96a4c5c53f902a3]::ops::function::Fn<(&'a std[ec4e911328de40a6]::panic::PanicHookInfo<'b>,), Output = ()> + core[a96a4c5c53f902a3]::marker::Sync + core[a96a4c5c53f902a3]::marker::Send> as core[a96a4c5c53f902a3]::ops::function::Fn<(&std[ec4e911328de40a6]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   12:     0x5b1bd3e7daec - test[30c43f9fd66fea90]::test_main_with_exit_callback::<test[30c43f9fd66fea90]::test_main::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x5b1bd3ef6d02 - <alloc[c960326de6de28e6]::boxed::Box<dyn for<'a, 'b> core[a96a4c5c53f902a3]::ops::function::Fn<(&'a std[ec4e911328de40a6]::panic::PanicHookInfo<'b>,), Output = ()> + core[a96a4c5c53f902a3]::marker::Sync + core[a96a4c5c53f902a3]::marker::Send> as core[a96a4c5c53f902a3]::ops::function::Fn<(&std[ec4e911328de40a6]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   14:     0x5b1bd3ef6d02 - std[ec4e911328de40a6]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5b1bd3edd868 - std[ec4e911328de40a6]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5b1bd3ed50b9 - std[ec4e911328de40a6]::sys::backtrace::__rust_end_short_backtrace::<std[ec4e911328de40a6]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5b1bd3ede57d - __rustc[aa69f48705c57ca8]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5b1bd3f12c8c - core[a96a4c5c53f902a3]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5b1bd3f12ba3 - core[a96a4c5c53f902a3]::panicking::assert_failed_inner
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/core/src/panicking.rs:434:23
[INFO] [stdout]   20:     0x5b1bd3e6c8ce - core[a96a4c5c53f902a3]::panicking::assert_failed::<bool, bool>
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/core/src/panicking.rs:394:5
[INFO] [stdout]   21:     0x5b1bd3e6dc2f - test_blargg[2474b18c64cc639d]::assert_result_ok
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/test_blargg.rs:153:5
[INFO] [stdout]   22:     0x5b1bd3e6dfdc - test_blargg[2474b18c64cc639d]::test_blargg_cpu_instrs_02
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/test_blargg.rs:39:5
[INFO] [stdout]   23:     0x5b1bd3e6d0f7 - test_blargg[2474b18c64cc639d]::test_blargg_cpu_instrs_02::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/test_blargg.rs:31:31
[INFO] [stdout]   24:     0x5b1bd3e717f6 - <test_blargg[2474b18c64cc639d]::test_blargg_cpu_instrs_02::{closure#0} as core[a96a4c5c53f902a3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x5b1bd3e71bcb - <fn() -> core[a96a4c5c53f902a3]::result::Result<(), alloc[c960326de6de28e6]::string::String> as core[a96a4c5c53f902a3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   26:     0x5b1bd3e71bcb - test[30c43f9fd66fea90]::__rust_begin_short_backtrace::<core[a96a4c5c53f902a3]::result::Result<(), alloc[c960326de6de28e6]::string::String>, fn() -> core[a96a4c5c53f902a3]::result::Result<(), alloc[c960326de6de28e6]::string::String>>
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/test/src/lib.rs:663:18
[INFO] [stdout]   27:     0x5b1bd3e7e5bb - test[30c43f9fd66fea90]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/test/src/lib.rs:686:74
[INFO] [stdout]   28:     0x5b1bd3e7e5bb - <core[a96a4c5c53f902a3]::panic::unwind_safe::AssertUnwindSafe<test[30c43f9fd66fea90]::run_test_in_process::{closure#0}> as core[a96a4c5c53f902a3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   29:     0x5b1bd3e7e5bb - std[ec4e911328de40a6]::panicking::catch_unwind::do_call::<core[a96a4c5c53f902a3]::panic::unwind_safe::AssertUnwindSafe<test[30c43f9fd66fea90]::run_test_in_process::{closure#0}>, core[a96a4c5c53f902a3]::result::Result<(), alloc[c960326de6de28e6]::string::String>>
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/panicking.rs:581:40
[INFO] [stdout]   30:     0x5b1bd3e7e5bb - std[ec4e911328de40a6]::panicking::catch_unwind::<core[a96a4c5c53f902a3]::result::Result<(), alloc[c960326de6de28e6]::string::String>, core[a96a4c5c53f902a3]::panic::unwind_safe::AssertUnwindSafe<test[30c43f9fd66fea90]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/panicking.rs:544:19
[INFO] [stdout]   31:     0x5b1bd3e7e5bb - std[ec4e911328de40a6]::panic::catch_unwind::<core[a96a4c5c53f902a3]::panic::unwind_safe::AssertUnwindSafe<test[30c43f9fd66fea90]::run_test_in_process::{closure#0}>, core[a96a4c5c53f902a3]::result::Result<(), alloc[c960326de6de28e6]::string::String>>
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/panic.rs:359:14
[INFO] [stdout]   32:     0x5b1bd3e7e5bb - test[30c43f9fd66fea90]::run_test_in_process
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/test/src/lib.rs:686:27
[INFO] [stdout]   33:     0x5b1bd3e7e5bb - test[30c43f9fd66fea90]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/test/src/lib.rs:607:43
[INFO] [stdout]   34:     0x5b1bd3e79cd4 - test[30c43f9fd66fea90]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/test/src/lib.rs:637:41
[INFO] [stdout]   35:     0x5b1bd3e79cd4 - std[ec4e911328de40a6]::sys::backtrace::__rust_begin_short_backtrace::<test[30c43f9fd66fea90]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   36:     0x5b1bd3e811c2 - std[ec4e911328de40a6]::thread::lifecycle::spawn_unchecked::<test[30c43f9fd66fea90]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   37:     0x5b1bd3e811c2 - <core[a96a4c5c53f902a3]::panic::unwind_safe::AssertUnwindSafe<std[ec4e911328de40a6]::thread::lifecycle::spawn_unchecked<test[30c43f9fd66fea90]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[a96a4c5c53f902a3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   38:     0x5b1bd3e811c2 - std[ec4e911328de40a6]::panicking::catch_unwind::do_call::<core[a96a4c5c53f902a3]::panic::unwind_safe::AssertUnwindSafe<std[ec4e911328de40a6]::thread::lifecycle::spawn_unchecked<test[30c43f9fd66fea90]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/panicking.rs:581:40
[INFO] [stdout]   39:     0x5b1bd3e811c2 - std[ec4e911328de40a6]::panicking::catch_unwind::<(), core[a96a4c5c53f902a3]::panic::unwind_safe::AssertUnwindSafe<std[ec4e911328de40a6]::thread::lifecycle::spawn_unchecked<test[30c43f9fd66fea90]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/panicking.rs:544:19
[INFO] [stdout]   40:     0x5b1bd3e811c2 - std[ec4e911328de40a6]::panic::catch_unwind::<core[a96a4c5c53f902a3]::panic::unwind_safe::AssertUnwindSafe<std[ec4e911328de40a6]::thread::lifecycle::spawn_unchecked<test[30c43f9fd66fea90]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/panic.rs:359:14
[INFO] [stdout]   41:     0x5b1bd3e811c2 - std[ec4e911328de40a6]::thread::lifecycle::spawn_unchecked::<test[30c43f9fd66fea90]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   42:     0x5b1bd3e811c2 - <std[ec4e911328de40a6]::thread::lifecycle::spawn_unchecked<test[30c43f9fd66fea90]::run_test::{closure#1}, ()>::{closure#1} as core[a96a4c5c53f902a3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   43:     0x5b1bd3efde9f - <alloc[c960326de6de28e6]::boxed::Box<dyn core[a96a4c5c53f902a3]::ops::function::FnOnce<(), Output = ()> + core[a96a4c5c53f902a3]::marker::Send> as core[a96a4c5c53f902a3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/alloc/src/boxed.rs:2240:9
[INFO] [stdout]   44:     0x5b1bd3efde9f - <std[ec4e911328de40a6]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   45:     0x7de4026a0aa4 - <unknown>
[INFO] [stdout]   46:     0x7de40272da64 - clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- test_blargg_cpu_instrs stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'test_blargg_cpu_instrs' (187) panicked at src/cpu.rs:713:41:
[INFO] [stdout] Memory address not supported: 0xff4d
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5b1bd3efe88a - std[ec4e911328de40a6]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5b1bd3efe88a - std[ec4e911328de40a6]::backtrace_rs::backtrace::trace_unsynchronized::<std[ec4e911328de40a6]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5b1bd3efe88a - std[ec4e911328de40a6]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5b1bd3efe88a - <<std[ec4e911328de40a6]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a96a4c5c53f902a3]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5b1bd3f1253a - <core[a96a4c5c53f902a3]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5b1bd3f1253a - core[a96a4c5c53f902a3]::fmt::write
[INFO] [stdout]    6:     0x5b1bd3f03112 - std[ec4e911328de40a6]::io::default_write_fmt::<alloc[c960326de6de28e6]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x5b1bd3f03112 - <alloc[c960326de6de28e6]::vec::Vec<u8> as std[ec4e911328de40a6]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x5b1bd3edd7af - <std[ec4e911328de40a6]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5b1bd3edd7af - std[ec4e911328de40a6]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5b1bd3ef6b49 - std[ec4e911328de40a6]::panicking::default_hook
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5b1bd3e7daec - <alloc[c960326de6de28e6]::boxed::Box<dyn for<'a, 'b> core[a96a4c5c53f902a3]::ops::function::Fn<(&'a std[ec4e911328de40a6]::panic::PanicHookInfo<'b>,), Output = ()> + core[a96a4c5c53f902a3]::marker::Sync + core[a96a4c5c53f902a3]::marker::Send> as core[a96a4c5c53f902a3]::ops::function::Fn<(&std[ec4e911328de40a6]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   12:     0x5b1bd3e7daec - test[30c43f9fd66fea90]::test_main_with_exit_callback::<test[30c43f9fd66fea90]::test_main::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x5b1bd3ef6d02 - <alloc[c960326de6de28e6]::boxed::Box<dyn for<'a, 'b> core[a96a4c5c53f902a3]::ops::function::Fn<(&'a std[ec4e911328de40a6]::panic::PanicHookInfo<'b>,), Output = ()> + core[a96a4c5c53f902a3]::marker::Sync + core[a96a4c5c53f902a3]::marker::Send> as core[a96a4c5c53f902a3]::ops::function::Fn<(&std[ec4e911328de40a6]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   14:     0x5b1bd3ef6d02 - std[ec4e911328de40a6]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5b1bd3edd868 - std[ec4e911328de40a6]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5b1bd3ed50b9 - std[ec4e911328de40a6]::sys::backtrace::__rust_end_short_backtrace::<std[ec4e911328de40a6]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5b1bd3ede57d - __rustc[aa69f48705c57ca8]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5b1bd3f12c8c - core[a96a4c5c53f902a3]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5b1bd3eb2a08 - <ruboy[4e4765ed15398c00]::memory::Mmu as core[a96a4c5c53f902a3]::ops::index::Index<u16>>::index
[INFO] [stdout]                                at /opt/rustwide/workdir/src/memory.rs:91:9
[INFO] [stdout]   20:     0x5b1bd3ec0dbc - <ruboy[4e4765ed15398c00]::cpu::Cpu>::get_operand
[INFO] [stdout]                                at /opt/rustwide/workdir/src/cpu.rs:713:41
[INFO] [stdout]   21:     0x5b1bd3ec12d3 - <ruboy[4e4765ed15398c00]::cpu::Cpu>::run
[INFO] [stdout]                                at /opt/rustwide/workdir/src/cpu.rs:420:38
[INFO] [stdout]   22:     0x5b1bd3e6dd27 - test_blargg[2474b18c64cc639d]::test_blargg_cpu_instrs
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/test_blargg.rs:13:9
[INFO] [stdout]   23:     0x5b1bd3e6d097 - test_blargg[2474b18c64cc639d]::test_blargg_cpu_instrs::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/test_blargg.rs:7:28
[INFO] [stdout]   24:     0x5b1bd3e71776 - <test_blargg[2474b18c64cc639d]::test_blargg_cpu_instrs::{closure#0} as core[a96a4c5c53f902a3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x5b1bd3e71bcb - <fn() -> core[a96a4c5c53f902a3]::result::Result<(), alloc[c960326de6de28e6]::string::String> as core[a96a4c5c53f902a3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   26:     0x5b1bd3e71bcb - test[30c43f9fd66fea90]::__rust_begin_short_backtrace::<core[a96a4c5c53f902a3]::result::Result<(), alloc[c960326de6de28e6]::string::String>, fn() -> core[a96a4c5c53f902a3]::result::Result<(), alloc[c960326de6de28e6]::string::String>>
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/test/src/lib.rs:663:18
[INFO] [stdout]   27:     0x5b1bd3e7e5bb - test[30c43f9fd66fea90]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/test/src/lib.rs:686:74
[INFO] [stdout]   28:     0x5b1bd3e7e5bb - <core[a96a4c5c53f902a3]::panic::unwind_safe::AssertUnwindSafe<test[30c43f9fd66fea90]::run_test_in_process::{closure#0}> as core[a96a4c5c53f902a3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   29:     0x5b1bd3e7e5bb - std[ec4e911328de40a6]::panicking::catch_unwind::do_call::<core[a96a4c5c53f902a3]::panic::unwind_safe::AssertUnwindSafe<test[30c43f9fd66fea90]::run_test_in_process::{closure#0}>, core[a96a4c5c53f902a3]::result::Result<(), alloc[c960326de6de28e6]::string::String>>
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/panicking.rs:581:40
[INFO] [stdout]   30:     0x5b1bd3e7e5bb - std[ec4e911328de40a6]::panicking::catch_unwind::<core[a96a4c5c53f902a3]::result::Result<(), alloc[c960326de6de28e6]::string::String>, core[a96a4c5c53f902a3]::panic::unwind_safe::AssertUnwindSafe<test[30c43f9fd66fea90]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/panicking.rs:544:19
[INFO] [stdout]   31:     0x5b1bd3e7e5bb - std[ec4e911328de40a6]::panic::catch_unwind::<core[a96a4c5c53f902a3]::panic::unwind_safe::AssertUnwindSafe<test[30c43f9fd66fea90]::run_test_in_process::{closure#0}>, core[a96a4c5c53f902a3]::result::Result<(), alloc[c960326de6de28e6]::string::String>>
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/panic.rs:359:14
[INFO] [stdout]   32:     0x5b1bd3e7e5bb - test[30c43f9fd66fea90]::run_test_in_process
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/test/src/lib.rs:686:27
[INFO] [stdout]   33:     0x5b1bd3e7e5bb - test[30c43f9fd66fea90]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/test/src/lib.rs:607:43
[INFO] [stdout]   34:     0x5b1bd3e79cd4 - test[30c43f9fd66fea90]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/test/src/lib.rs:637:41
[INFO] [stdout]   35:     0x5b1bd3e79cd4 - std[ec4e911328de40a6]::sys::backtrace::__rust_begin_short_backtrace::<test[30c43f9fd66fea90]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   36:     0x5b1bd3e811c2 - std[ec4e911328de40a6]::thread::lifecycle::spawn_unchecked::<test[30c43f9fd66fea90]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   37:     0x5b1bd3e811c2 - <core[a96a4c5c53f902a3]::panic::unwind_safe::AssertUnwindSafe<std[ec4e911328de40a6]::thread::lifecycle::spawn_unchecked<test[30c43f9fd66fea90]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[a96a4c5c53f902a3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   38:     0x5b1bd3e811c2 - std[ec4e911328de40a6]::panicking::catch_unwind::do_call::<core[a96a4c5c53f902a3]::panic::unwind_safe::AssertUnwindSafe<std[ec4e911328de40a6]::thread::lifecycle::spawn_unchecked<test[30c43f9fd66fea90]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/panicking.rs:581:40
[INFO] [stdout]   39:     0x5b1bd3e811c2 - std[ec4e911328de40a6]::panicking::catch_unwind::<(), core[a96a4c5c53f902a3]::panic::unwind_safe::AssertUnwindSafe<std[ec4e911328de40a6]::thread::lifecycle::spawn_unchecked<test[30c43f9fd66fea90]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/panicking.rs:544:19
[INFO] [stdout]   40:     0x5b1bd3e811c2 - std[ec4e911328de40a6]::panic::catch_unwind::<core[a96a4c5c53f902a3]::panic::unwind_safe::AssertUnwindSafe<std[ec4e911328de40a6]::thread::lifecycle::spawn_unchecked<test[30c43f9fd66fea90]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/panic.rs:359:14
[INFO] [stdout]   41:     0x5b1bd3e811c2 - std[ec4e911328de40a6]::thread::lifecycle::spawn_unchecked::<test[30c43f9fd66fea90]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   42:     0x5b1bd3e811c2 - <std[ec4e911328de40a6]::thread::lifecycle::spawn_unchecked<test[30c43f9fd66fea90]::run_test::{closure#1}, ()>::{closure#1} as core[a96a4c5c53f902a3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   43:     0x5b1bd3efde9f - <alloc[c960326de6de28e6]::boxed::Box<dyn core[a96a4c5c53f902a3]::ops::function::FnOnce<(), Output = ()> + core[a96a4c5c53f902a3]::marker::Send> as core[a96a4c5c53f902a3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/alloc/src/boxed.rs:2240:9
[INFO] [stdout]   44:     0x5b1bd3efde9f - <std[ec4e911328de40a6]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/0abe69e6c16114311cc2700e972492e64d69c28f/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   45:     0x7de4026a0aa4 - <unknown>
[INFO] [stdout]   46:     0x7de40272da64 - clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     test_blargg_cpu_instrs
[INFO] [stdout]     test_blargg_cpu_instrs_02
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 10 passed; 2 failed; 0 ignored; 0 measured; 0 filtered out; finished in 3.88s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "1af45c31d7b4e3ec4184ee971a0155d34dcdf55aa5abe93e95a74bd6c570880a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "1af45c31d7b4e3ec4184ee971a0155d34dcdf55aa5abe93e95a74bd6c570880a", kill_on_drop: false }`
[INFO] [stdout] 1af45c31d7b4e3ec4184ee971a0155d34dcdf55aa5abe93e95a74bd6c570880a
